[INFO] fetching crate sip-header 0.2.2...
[INFO] testing sip-header-0.2.2 against master#1f7f8ea0721a3b1eb73e6c6d25cccb371434b320 for pr-154065-1
[INFO] extracting crate sip-header 0.2.2 into /workspace/builds/worker-3-tc1/source
[INFO] started tweaking crates.io crate sip-header 0.2.2
[INFO] finished tweaking crates.io crate sip-header 0.2.2
[INFO] tweaked toml for crates.io crate sip-header 0.2.2 written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate sip-header 0.2.2 on toolchain 1f7f8ea0721a3b1eb73e6c6d25cccb371434b320
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate sip-header 0.2.2 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded sip-uri v0.2.2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] c6632c8eaf99aa5d424a835b48c86fee06f3001e309e32d5eb27c59d710bab9f
[INFO] running `Command { std: "docker" "start" "-a" "c6632c8eaf99aa5d424a835b48c86fee06f3001e309e32d5eb27c59d710bab9f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c6632c8eaf99aa5d424a835b48c86fee06f3001e309e32d5eb27c59d710bab9f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c6632c8eaf99aa5d424a835b48c86fee06f3001e309e32d5eb27c59d710bab9f", kill_on_drop: false }`
[INFO] [stdout] c6632c8eaf99aa5d424a835b48c86fee06f3001e309e32d5eb27c59d710bab9f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ea58d8ae360c5cd10a8b8a30ff38782af26d6114fddf0ed3113ffd33a85c2d7e
[INFO] running `Command { std: "docker" "start" "-a" "ea58d8ae360c5cd10a8b8a30ff38782af26d6114fddf0ed3113ffd33a85c2d7e", kill_on_drop: false }`
[INFO] [stderr]    Compiling sip-uri v0.2.2
[INFO] [stderr]    Compiling sip-header v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1.53s
[INFO] running `Command { std: "docker" "inspect" "ea58d8ae360c5cd10a8b8a30ff38782af26d6114fddf0ed3113ffd33a85c2d7e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ea58d8ae360c5cd10a8b8a30ff38782af26d6114fddf0ed3113ffd33a85c2d7e", kill_on_drop: false }`
[INFO] [stdout] ea58d8ae360c5cd10a8b8a30ff38782af26d6114fddf0ed3113ffd33a85c2d7e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 865c1826bbe1181d0e1363f78e5345ec07aed26ca1de1279c0b1cac823978ed1
[INFO] running `Command { std: "docker" "start" "-a" "865c1826bbe1181d0e1363f78e5345ec07aed26ca1de1279c0b1cac823978ed1", kill_on_drop: false }`
[INFO] [stderr]    Compiling quick-xml v0.39.2
[INFO] [stderr]    Compiling sip-header v0.2.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3.73s
[INFO] running `Command { std: "docker" "inspect" "865c1826bbe1181d0e1363f78e5345ec07aed26ca1de1279c0b1cac823978ed1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "865c1826bbe1181d0e1363f78e5345ec07aed26ca1de1279c0b1cac823978ed1", kill_on_drop: false }`
[INFO] [stdout] 865c1826bbe1181d0e1363f78e5345ec07aed26ca1de1279c0b1cac823978ed1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4f1df2acc8527f3edda7ef93fbf1e82e5d7b0145bda9ca1abd386e37a173b8e7
[INFO] running `Command { std: "docker" "start" "-a" "4f1df2acc8527f3edda7ef93fbf1e82e5d7b0145bda9ca1abd386e37a173b8e7", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.08s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sip_header-89e5a0f41ef531a8)
[INFO] [stdout] 
[INFO] [stdout] running 142 tests
[INFO] [stdout] test call_info::tests::entry_display_contains_all_metadata ... ok
[INFO] [stdout] test call_info::tests::entry_no_metadata ... ok
[INFO] [stdout] test call_info::tests::entry_display_metadata_no_trailing_semicolon ... ok
[INFO] [stdout] test call_info::tests::entry_no_metadata_trailing_semicolon ... ok
[INFO] [stdout] test call_info::tests::display_roundtrip ... ok
[INFO] [stdout] test call_info::tests::entry_display_no_trailing_semicolon ... ok
[INFO] [stdout] test call_info::tests::entry_no_value_metadata ... ok
[INFO] [stdout] test call_info::tests::entry_strips_angle_brackets ... ok
[INFO] [stdout] test call_info::tests::entry_uppercase_metadata_key_lowercased ... ok
[INFO] [stdout] test call_info::tests::display_comma_count_matches_entries ... ok
[INFO] [stdout] test call_info::tests::full_fixture_legacy_eido_purpose ... ok
[INFO] [stdout] test call_info::tests::entry_two_metadata_items ... ok
[INFO] [stdout] test call_info::tests::filter_entries_by_param ... ok
[INFO] [stdout] test call_info::tests::find_by_purpose ... ok
[INFO] [stdout] test call_info::tests::full_fixture_nena_prefix_callid ... ok
[INFO] [stdout] test call_info::tests::metadata_param_lookup ... ok
[INFO] [stdout] test call_info::tests::param_lookup_by_purpose ... ok
[INFO] [stdout] test call_info::tests::parse_comma_separated ... ok
[INFO] [stdout] test call_info::tests::parse_full_fixture_all_entries ... ok
[INFO] [stdout] test call_info::tests::full_fixture_trailing_semicolon_with_site ... ok
[INFO] [stdout] test geolocation::tests::display_roundtrip ... ok
[INFO] [stdout] test geolocation::tests::empty_brackets_skipped ... ok
[INFO] [stdout] test geolocation::tests::empty_input ... ok
[INFO] [stdout] test geolocation::tests::multiple_cids ... ok
[INFO] [stdout] test geolocation::tests::parse_cid_and_url ... ok
[INFO] [stdout] test geolocation::tests::single_cid ... ok
[INFO] [stdout] test geolocation::tests::single_url ... ok
[INFO] [stdout] test header::compact_form_tests::compact_form_absent ... ok
[INFO] [stdout] test header::compact_form_tests::all_compact_forms_resolve ... ok
[INFO] [stdout] test header::compact_form_tests::compact_form_roundtrip ... ok
[INFO] [stdout] test header::compact_form_tests::from_compact_known ... ok
[INFO] [stdout] test header::compact_form_tests::parse_name_compact ... ok
[INFO] [stdout] test header::compact_form_tests::parse_name_full ... ok
[INFO] [stdout] test header::compact_form_tests::parse_name_unknown ... ok
[INFO] [stdout] test header::compact_form_tests::from_compact_unknown ... ok
[INFO] [stdout] test header::multi_valued_tests::extension_multi_valued_headers ... ok
[INFO] [stdout] test header::multi_valued_tests::rfc3261_multi_valued_headers ... ok
[INFO] [stdout] test header::multi_valued_tests::single_valued_headers ... ok
[INFO] [stdout] test header::special_case_tests::cseq_variants ... ok
[INFO] [stdout] test header::special_case_tests::p_header_variants ... ok
[INFO] [stdout] test header::special_case_tests::rack_rseq_variants ... ok
[INFO] [stdout] test header::special_case_tests::user_to_user_variants ... ok
[INFO] [stdout] test header::tests::as_ref_str ... ok
[INFO] [stdout] test header::special_case_tests::www_authenticate_variants ... ok
[INFO] [stdout] test header::tests::call_info_absent ... ok
[INFO] [stdout] test header::tests::display_round_trip ... ok
[INFO] [stdout] test header::tests::call_info_raw_lookup ... ok
[INFO] [stdout] test header::tests::call_info_typed ... ok
[INFO] [stdout] test header::tests::extract_from_sip_message ... ok
[INFO] [stdout] test header::tests::extract_from_missing ... ok
[INFO] [stdout] test header::tests::from_str_case_insensitive ... ok
[INFO] [stdout] test header::tests::from_str_unknown ... ok
[INFO] [stdout] test header::tests::history_info_raw_lookup ... ok
[INFO] [stdout] test header::tests::history_info_typed ... ok
[INFO] [stdout] test header::tests::from_str_round_trip_all ... ok
[INFO] [stdout] test header::tests::history_info_absent ... ok
[INFO] [stdout] test header::tests::missing_headers_return_none ... ok
[INFO] [stdout] test header::tests::p_asserted_identity_absent ... ok
[INFO] [stdout] test call_info::tests::empty_input ... ok
[INFO] [stdout] test call_info::tests::entry_display_no_value_key ... ok
[INFO] [stdout] test header::tests::p_asserted_identity_raw_lookup ... ok
[INFO] [stdout] test header::tests::p_asserted_identity_typed ... ok
[INFO] [stdout] test header_addr::tests::angle_bracket_no_name_multiple_params ... ok
[INFO] [stdout] test header_addr::tests::bare_addr_spec_no_params ... ok
[INFO] [stdout] test header_addr::tests::case_insensitive_param_lookup ... ok
[INFO] [stdout] test header_addr::tests::display_roundtrip_bare_uri ... ok
[INFO] [stdout] test header::tests::sip_header_by_enum ... ok
[INFO] [stdout] test header_addr::tests::builder_new ... ok
[INFO] [stdout] test header_addr::tests::builder_with_display_name_and_params ... ok
[INFO] [stdout] test header_addr::tests::display_roundtrip_escaped_quotes ... ok
[INFO] [stdout] test header_addr::tests::display_roundtrip_flag_param ... ok
[INFO] [stdout] test header_addr::tests::display_roundtrip_quoted_name_with_params ... ok
[INFO] [stdout] test header_addr::tests::empty_input_fails ... ok
[INFO] [stdout] test header_addr::tests::display_roundtrip_name_requiring_quotes ... ok
[INFO] [stdout] test header_addr::tests::display_roundtrip_percent_encoded_params ... ok
[INFO] [stdout] test header_addr::tests::display_roundtrip_no_name_with_params ... ok
[INFO] [stdout] test header_addr::tests::flag_param_no_value ... ok
[INFO] [stdout] test header_addr::tests::escaped_quotes_in_display_name ... ok
[INFO] [stdout] test header_addr::tests::builder_flag_param ... ok
[INFO] [stdout] test header_addr::tests::param_invalid_utf8_returns_err ... ok
[INFO] [stdout] test header_addr::tests::parse_list_empty_returns_empty ... ok
[INFO] [stdout] test header_addr::tests::parse_list_propagates_parse_error ... ok
[INFO] [stdout] test header_addr::tests::parse_list_single_entry ... ok
[INFO] [stdout] test header_addr::tests::ng911_refer_to_serviceurn ... ok
[INFO] [stdout] test header_addr::tests::parse_list_multiple_entries ... ok
[INFO] [stdout] test header_addr::tests::param_iso_8859_fallback_to_raw ... ok
[INFO] [stdout] test header_addr::tests::p_asserted_identity_uri_params_no_header_params ... ok
[INFO] [stdout] test header_addr::tests::quoted_display_name_with_tag ... ok
[INFO] [stdout] test header_addr::tests::params_iterator ... ok
[INFO] [stdout] test header_addr::tests::tag_convenience_accessor ... ok
[INFO] [stdout] test header_addr::tests::trailing_semicolon_ignored ... ok
[INFO] [stdout] test header_addr::tests::tel_uri_with_header_params ... ok
[INFO] [stdout] test header_addr::tests::urn_uri_no_params ... ok
[INFO] [stdout] test header_addr::tests::unquoted_display_name_with_params ... ok
[INFO] [stdout] test history_info::tests::display_roundtrip_real_world ... ok
[INFO] [stdout] test history_info::tests::empty_input ... ok
[INFO] [stdout] test history_info::tests::display_roundtrip_simple ... ok
[INFO] [stdout] test history_info::tests::index_absent ... ok
[INFO] [stdout] test history_info::tests::index_hierarchical ... ok
[INFO] [stdout] test history_info::tests::display_entry_count_matches_commas ... ok
[INFO] [stdout] test history_info::tests::parse_reason_no_text ... ok
[INFO] [stdout] test history_info::tests::index_simple ... ok
[INFO] [stdout] test history_info::tests::parse_reason_full ... ok
[INFO] [stdout] test history_info::tests::into_entries ... ok
[INFO] [stdout] test history_info::tests::iter_by_ref ... ok
[INFO] [stdout] test history_info::tests::parse_reason_protocol_only ... ok
[INFO] [stdout] test history_info::tests::parse_reason_unquoted_text ... ok
[INFO] [stdout] test history_info::tests::parse_two_entries ... ok
[INFO] [stdout] test history_info::tests::parse_three_entries ... ok
[INFO] [stdout] test history_info::tests::reason_multiple_entries ... ok
[INFO] [stdout] test history_info::tests::reason_absent_returns_none ... ok
[INFO] [stdout] test history_info::tests::parse_single_entry ... ok
[INFO] [stdout] test history_info::tests::uri_with_params ... ok
[INFO] [stdout] test history_info::tests::reason_parsed_sip ... ok
[INFO] [stdout] test history_info::tests::reason_raw_absent ... ok
[INFO] [stdout] test history_info::tests::reason_parsed_route_action ... ok
[INFO] [stdout] test history_info::tests::uri_with_user ... ok
[INFO] [stdout] test history_info::tests::reason_raw_present ... ok
[INFO] [stdout] test message::tests::case_insensitive_name ... ok
[INFO] [stdout] test history_info::tests::uri_without_user ... ok
[INFO] [stdout] test message::tests::bare_lf_line_endings ... ok
[INFO] [stdout] test message::tests::compact_form_mixed_with_full ... ok
[INFO] [stdout] test message::tests::compact_form_case_insensitive ... ok
[INFO] [stdout] test message::tests::basic_extraction ... ok
[INFO] [stdout] test message::tests::compact_form_from ... ok
[INFO] [stdout] test message::tests::compact_form_via ... ok
[INFO] [stdout] test message::tests::empty_header_value ... ok
[INFO] [stdout] test message::tests::compact_form_unknown_single_char ... ok
[INFO] [stdout] test message::tests::extract_and_parse_call_info ... ok
[INFO] [stdout] test message::tests::extract_and_parse_geolocation ... ok
[INFO] [stdout] test message::tests::header_folding ... ok
[INFO] [stdout] test message::tests::empty_message ... ok
[INFO] [stdout] test message::tests::folding_on_multiple_occurrence ... ok
[INFO] [stdout] test message::tests::extract_and_parse_p_asserted_identity ... ok
[INFO] [stdout] test message::tests::request_line_not_matched ... ok
[INFO] [stdout] test message::tests::stops_at_blank_line ... ok
[INFO] [stdout] test message::tests::tab_folding ... ok
[INFO] [stdout] test message::tests::value_leading_whitespace_trimmed ... ok
[INFO] [stdout] test call_info::tests::entry_empty_value_metadata ... ok
[INFO] [stdout] test message::tests::multiple_occurrences_concatenated ... ok
[INFO] [stdout] test message::tests::extract_and_parse_from_to ... ok
[INFO] [stdout] test message::tests::missing_header_returns_none ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 142 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests sip_header
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test src/macros.rs - macros::define_header_enum (line 12) ... ignored
[INFO] [stdout] test src/history_info.rs - history_info::HistoryInfo (line 199) ... ok
[INFO] [stdout] test src/header_addr.rs - header_addr::SipHeaderAddr (line 35) ... ok
[INFO] [stdout] test src/geolocation.rs - geolocation::SipGeolocation (line 35) ... ok
[INFO] [stdout] test src/call_info.rs - call_info::SipCallInfo (line 55) ... ok
[INFO] [stdout] test src/header.rs - header::SipHeaderLookup (line 441) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.51s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "4f1df2acc8527f3edda7ef93fbf1e82e5d7b0145bda9ca1abd386e37a173b8e7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4f1df2acc8527f3edda7ef93fbf1e82e5d7b0145bda9ca1abd386e37a173b8e7", kill_on_drop: false }`
[INFO] [stdout] 4f1df2acc8527f3edda7ef93fbf1e82e5d7b0145bda9ca1abd386e37a173b8e7
